04-24 13:28:54 D/ModuleListener: ModuleListener.testStarted(com.google.android.assistant.tvts.AssistantLatencyTestBench#runAssistantTests) on SKBFXYZO0DTQ
04-24 13:28:54 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 13:28:54 D/DeviceHostUtils: apiLevel: 31
04-24 13:28:54 D/RunUtil: Running command null without timeout.
04-24 13:28:54 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 13:28:54 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 13:28:54 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 13:28:54 I/AppRunnerUtils: Service PID = 4633
04-24 13:28:54 D/RunUtil: Running command null without timeout.
04-24 13:28:54 D/AppRunnerUtils: Checking service: com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 13:28:54 D/AppRunnerUtils: Running the following command: dumpsys activity service com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService
04-24 13:28:54 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, activity, service, com.google.android.katniss/.search.serviceapi.KatnissVoiceInteractionService] with timeout: 2m 0s
04-24 13:28:54 I/AppRunnerUtils: Service PID = 4633
04-24 13:28:54 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 13:28:54 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 13:28:54 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:28:54 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:28:55 I/DeviceStateMonitor: Waiting 359918 ms for device SKBFXYZO0DTQ package manager
04-24 13:28:55 I/NativeDeviceStateMonitor: Waiting 359760 ms for device SKBFXYZO0DTQ external store
04-24 13:28:55 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 13:28:55 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, getprop, ro.build.version.codename] with timeout: 45s
04-24 13:28:55 D/NativeDevice: Using property ro.build.version.sdk=31 from cache.
04-24 13:28:55 D/WifiUtil.apk4819369773083760674.apk: Uploading WifiUtil.apk4819369773083760674.apk onto device 'SKBFXYZO0DTQ'
04-24 13:28:55 D/Device: Uploading file onto device 'SKBFXYZO0DTQ'
04-24 13:28:56 D/RunUtil: Running command [aapt, dump, badging, /data/tmp/b622cc93-c09c-48a6-a768-3ed6f6859877/tmp/WifiUtil.apk4819369773083760674.apk] with timeout: 1m 0s
04-24 13:28:56 D/RunUtil: Running command [aapt, dump, xmltree, /data/tmp/b622cc93-c09c-48a6-a768-3ed6f6859877/tmp/WifiUtil.apk4819369773083760674.apk, AndroidManifest.xml] with timeout: 1m 0s
04-24 13:28:56 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, appops, write-settings] with timeout: 2m 0s
04-24 13:28:59 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:28:59 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:28:59 D/AssistantTestUtils: Successfully triggered assistant setup.
04-24 13:28:59 I/AssistantLatencyTestBench: Assistant OOBE skipping required: true
04-24 13:28:59 I/KeyCodeUtils: Sending keyevent KEYCODE_BACK - intValue: 4
04-24 13:28:59 D/AppRunnerUtils: foregroundActivitySet(): [com.skb.tv/com.skb.google.tv.main.MainActivity]
04-24 13:29:00 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.skb.google.tv.main.MainActivity.
04-24 13:29:00 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 13:29:00 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 13:29:01 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:01 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:01 I/DeviceStateMonitor: Waiting 359902 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:01 I/NativeDeviceStateMonitor: Waiting 359768 ms for device SKBFXYZO0DTQ external store
04-24 13:29:03 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity]
04-24 13:29:04 D/AppRunnerUtils: getActivityShownByPackage(): ActivityName: com.google.android.apps.tvsearch.setup.AssistantSetupActivity.
04-24 13:29:04 D/AssistantTestUtils: Assistant successfully launched: true
04-24 13:29:04 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 13:29:04 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 13:29:05 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:05 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:05 I/DeviceStateMonitor: Waiting 359933 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:05 I/NativeDeviceStateMonitor: Waiting 359841 ms for device SKBFXYZO0DTQ external store
04-24 13:29:07 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:07 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:29:07 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:07 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:07 I/DeviceStateMonitor: Waiting 359958 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:07 I/NativeDeviceStateMonitor: Waiting 359897 ms for device SKBFXYZO0DTQ external store
04-24 13:29:09 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:09 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:29:09 D/AssistantTestUtils: Accepting all in OOBE...
04-24 13:29:09 I/KeyCodeUtils: Sending keyevent KEYCODE_ENTER - intValue: 66
04-24 13:29:10 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:10 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:10 I/DeviceStateMonitor: Waiting 359933 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:10 I/NativeDeviceStateMonitor: Waiting 359841 ms for device SKBFXYZO0DTQ external store
04-24 13:29:12 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:12 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantDataSharingConsentActivity
04-24 13:29:12 I/KeyCodeUtils: Sending keyevent KEYCODE_ENTER - intValue: 66
04-24 13:29:13 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:13 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:13 I/DeviceStateMonitor: Waiting 359958 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:13 I/NativeDeviceStateMonitor: Waiting 359871 ms for device SKBFXYZO0DTQ external store
04-24 13:29:15 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:15 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:29:15 I/KeyCodeUtils: Sending keyevent KEYCODE_ENTER - intValue: 66
04-24 13:29:16 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:16 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:16 I/DeviceStateMonitor: Waiting 359958 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:16 I/NativeDeviceStateMonitor: Waiting 359891 ms for device SKBFXYZO0DTQ external store
04-24 13:29:18 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:18 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:29:18 I/KeyCodeUtils: Sending keyevent KEYCODE_ENTER - intValue: 66
04-24 13:29:18 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:18 I/NativeDeviceStateMonitor: Waiting 359999 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:18 I/DeviceStateMonitor: Waiting 359933 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:18 I/NativeDeviceStateMonitor: Waiting 359846 ms for device SKBFXYZO0DTQ external store
04-24 13:29:20 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:20 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.setup.AssistantSetupActivity
04-24 13:29:20 I/KeyCodeUtils: Sending keyevent KEYCODE_ENTER - intValue: 66
04-24 13:29:21 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:21 I/NativeDeviceStateMonitor: Waiting 360000 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:21 I/DeviceStateMonitor: Waiting 359934 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:21 I/NativeDeviceStateMonitor: Waiting 359867 ms for device SKBFXYZO0DTQ external store
04-24 13:29:23 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:23 D/AppRunnerUtils: com.google.android.youtube.tv/com.google.android.apps.youtube.tv.activity.StandalonePlayerActivity
04-24 13:29:23 D/RunUtil: Running command null without timeout.
04-24 13:29:23 D/AppRunnerUtils: getHomeActivityName(): launcherActivityName: com.skb.tv/com.skb.google.tv.main.MainActivity
04-24 13:29:24 D/AppRunnerUtils: getHomeActivityName(): launcherActivityName: com.skb.tv/com.skb.google.tv.main.MainActivity
04-24 13:29:24 D/AppRunnerUtils: pressHomeUntilBackHome(): poll time: 500  totalTime: 4000  attempts: 8
04-24 13:29:24 D/RunUtil: Running command null without timeout.
04-24 13:29:24 D/AppRunnerUtils: foregroundActivitySet(): [com.google.android.youtube.tv/com.google.android.apps.youtube.tv.activity.StandalonePlayerActivity]
04-24 13:29:24 I/KeyCodeUtils: Sending keyevent KEYCODE_HOME - intValue: 3
04-24 13:29:24 D/AppRunnerUtils: [com.google.android.youtube.tv/com.google.android.apps.youtube.tv.activity.StandalonePlayerActivity]
04-24 13:29:24 D/RunUtil: operation failed, waiting for 500 ms
04-24 13:29:24 D/RunUtil: Running command null without timeout.
04-24 13:29:24 D/AppRunnerUtils: foregroundActivitySet(): [com.skb.tv/com.skb.google.tv.main.MainActivity]
04-24 13:29:25 D/AppRunnerUtils: foregroundActivitySet(): [com.skb.tv/com.skb.google.tv.main.MainActivity]
04-24 13:29:25 D/AppRunnerUtils: Running the following command: am start --es query Weather -p com.google.android.katniss -c android.intent.category.DEFAULT -a android.intent.action.ASSIST
04-24 13:29:25 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, am, start, --es, query, Weather, -p, com.google.android.katniss, -c, android.intent.category.DEFAULT, -a, android.intent.action.ASSIST] with timeout: 2m 0s
04-24 13:29:25 I/NativeDeviceStateMonitor: Device SKBFXYZO0DTQ is already ONLINE
04-24 13:29:25 I/NativeDeviceStateMonitor: Waiting 359999 ms for device SKBFXYZO0DTQ boot complete
04-24 13:29:25 I/DeviceStateMonitor: Waiting 359908 ms for device SKBFXYZO0DTQ package manager
04-24 13:29:25 I/NativeDeviceStateMonitor: Waiting 359714 ms for device SKBFXYZO0DTQ external store
04-24 13:29:28 D/RunUtil: Running command [adb, -s, SKBFXYZO0DTQ, shell, dumpsys, window, windows, --proto] with timeout: 2m 0s
04-24 13:29:28 D/AppRunnerUtils: com.google.android.katniss/com.google.android.apps.tvsearch.results.activity.SearchResultActivity
04-24 13:29:28 D/AssistantTestUtils: AssistantSearchActivity: SearchResultActivity
04-24 13:29:28 D/AssistantTestUtils: Successfully triggered assistant search.
04-24 15:15:05 D/PrettyTestEventLogger: 
==================== com.google.android.assistant.tvts.AssistantLatencyTestBench#runAssistantTests ENDED: Wed Apr 24 15:15:05 KST 2024 ====================
